Description: rados/mgr/{clusters/{2-node-mgr} debug/mgr mgr_ttl_cache/enable mon_election/connectivity random-objectstore$/{bluestore-comp-zstd} supported-random-distro$/{centos_8} tasks/module_selftest}

Log: http://qa-proxy.ceph.com/teuthology/yuriw-2023-01-27_01:16:03-rados-wip-yuri6-testing-2023-01-26-0941-distro-default-smithi/7140823/teuthology.log

Failure Reason:

SELinux denials found on ubuntu@smithi188.front.sepia.ceph.com: ['type=AVC msg=audit(1674875106.111:16987): avc: denied { read } for pid=93977 comm="rpm" name="Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874734.470:212): avc: denied { open } for pid=3840 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874734.470:212): avc: denied { read } for pid=3840 comm="rpm" name="Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874733.638:209): avc: denied { lock } for pid=2658 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.828:23659): avc: denied { map } for pid=141442 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=525267 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.442:23646): avc: denied { search } for pid=1531 comm=72733A6D61696E20513A526567 name="cephtest" dev="sda1" ino=525248 scontext=system_u:system_r:syslogd_t:s0 tcontext=unconfined_u:object_r:user_home_t:s0 tclass=dir permissive=1', 'type=AVC msg=audit(1674874734.470:213): avc: denied { lock } for pid=3840 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674875105.753:16956): avc: denied { read } for pid=748 comm="sssd" name="resolv.conf" dev="sda1" ino=525297 scontext=system_u:system_r:sssd_t:s0 tcontext=unconfined_u:object_r:user_home_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674875106.111:16989): avc: denied { map } for pid=93977 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=525267 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.828:23657): avc: denied { read } for pid=141442 comm="rpm" name="Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874733.633:208): avc: denied { read } for pid=2658 comm="rpm" name="Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674875106.111:16987): avc: denied { open } for pid=93977 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674875106.111:16988): avc: denied { lock } for pid=93977 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874733.633:208): avc: denied { open } for pid=2658 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876542.084:23293): avc: denied { read } for pid=138963 comm="rpm" name="Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876542.084:23295): avc: denied { map } for pid=138963 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=525267 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.828:23657): avc: denied { open } for pid=141442 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874733.643:210): avc: denied { map } for pid=2658 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=98535 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874734.470:214): avc: denied { map } for pid=3840 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=98535 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876542.084:23294): avc: denied { lock } for pid=138963 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876542.084:23293): avc: denied { open } for pid=138963 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.828:23658): avc: denied { lock } for pid=141442 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876541.662:23284): avc: denied { search } for pid=1531 comm=72733A6D61696E20513A526567 name="cephtest" dev="sda1" ino=525248 scontext=system_u:system_r:syslogd_t:s0 tcontext=unconfined_u:object_r:user_home_t:s0 tclass=dir permissive=1']

  • log_href: http://qa-proxy.ceph.com/teuthology/yuriw-2023-01-27_01:16:03-rados-wip-yuri6-testing-2023-01-26-0941-distro-default-smithi/7140823/teuthology.log
  • archive_path: /home/teuthworker/archive/yuriw-2023-01-27_01:16:03-rados-wip-yuri6-testing-2023-01-26-0941-distro-default-smithi/7140823
  • description: rados/mgr/{clusters/{2-node-mgr} debug/mgr mgr_ttl_cache/enable mon_election/connectivity random-objectstore$/{bluestore-comp-zstd} supported-random-distro$/{centos_8} tasks/module_selftest}
  • duration: 0:31:40
  • email: yweinstein@radhat.com
  • failure_reason: SELinux denials found on ubuntu@smithi188.front.sepia.ceph.com: ['type=AVC msg=audit(1674875106.111:16987): avc: denied { read } for pid=93977 comm="rpm" name="Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874734.470:212): avc: denied { open } for pid=3840 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874734.470:212): avc: denied { read } for pid=3840 comm="rpm" name="Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874733.638:209): avc: denied { lock } for pid=2658 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.828:23659): avc: denied { map } for pid=141442 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=525267 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.442:23646): avc: denied { search } for pid=1531 comm=72733A6D61696E20513A526567 name="cephtest" dev="sda1" ino=525248 scontext=system_u:system_r:syslogd_t:s0 tcontext=unconfined_u:object_r:user_home_t:s0 tclass=dir permissive=1', 'type=AVC msg=audit(1674874734.470:213): avc: denied { lock } for pid=3840 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674875105.753:16956): avc: denied { read } for pid=748 comm="sssd" name="resolv.conf" dev="sda1" ino=525297 scontext=system_u:system_r:sssd_t:s0 tcontext=unconfined_u:object_r:user_home_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674875106.111:16989): avc: denied { map } for pid=93977 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=525267 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.828:23657): avc: denied { read } for pid=141442 comm="rpm" name="Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874733.633:208): avc: denied { read } for pid=2658 comm="rpm" name="Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674875106.111:16987): avc: denied { open } for pid=93977 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674875106.111:16988): avc: denied { lock } for pid=93977 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874733.633:208): avc: denied { open } for pid=2658 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=98534 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876542.084:23293): avc: denied { read } for pid=138963 comm="rpm" name="Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876542.084:23295): avc: denied { map } for pid=138963 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=525267 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.828:23657): avc: denied { open } for pid=141442 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874733.643:210): avc: denied { map } for pid=2658 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=98535 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674874734.470:214): avc: denied { map } for pid=3840 comm="rpm" path="/var/lib/rpm/Name" dev="sda1" ino=98535 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876542.084:23294): avc: denied { lock } for pid=138963 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876542.084:23293): avc: denied { open } for pid=138963 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876611.828:23658): avc: denied { lock } for pid=141442 comm="rpm" path="/var/lib/rpm/Packages" dev="sda1" ino=525266 scontext=system_u:system_r:setroubleshootd_t:s0 tcontext=unconfined_u:object_r:var_lib_t:s0 tclass=file permissive=1', 'type=AVC msg=audit(1674876541.662:23284): avc: denied { search } for pid=1531 comm=72733A6D61696E20513A526567 name="cephtest" dev="sda1" ino=525248 scontext=system_u:system_r:syslogd_t:s0 tcontext=unconfined_u:object_r:user_home_t:s0 tclass=dir permissive=1']
  • flavor: default
  • job_id: 7140823
  • kernel:
    • kdb: True
    • sha1: distro
  • last_in_suite: False
  • machine_type: smithi
  • name: yuriw-2023-01-27_01:16:03-rados-wip-yuri6-testing-2023-01-26-0941-distro-default-smithi
  • nuke_on_error: True
  • os_type: centos
  • os_version: 8.stream
  • overrides:
    • admin_socket:
      • branch: wip-yuri6-testing-2023-01-26-0941
    • ceph:
      • conf:
        • client:
          • debug client: 20
          • debug mgrc: 20
          • debug ms: 1
        • global:
          • mon election default strategy: 3
        • mds:
          • debug mgrc: 20
        • mgr:
          • debug client: 20
          • debug mgr: 20
          • debug ms: 1
          • mgr ttl cache expire seconds: 5
        • mon:
          • debug mon: 20
          • debug ms: 1
          • debug paxos: 20
        • osd:
          • bluestore block size: 96636764160
          • bluestore compression algorithm: zstd
          • bluestore compression mode: aggressive
          • bluestore fsck on mount: True
          • debug bluefs: 20
          • debug bluestore: 20
          • debug mgrc: 20
          • debug ms: 1
          • debug osd: 20
          • debug rocksdb: 10
          • mon osd backfillfull_ratio: 0.85
          • mon osd full ratio: 0.9
          • mon osd nearfull ratio: 0.8
          • osd failsafe full ratio: 0.95
          • osd objectstore: bluestore
      • flavor: default
      • fs: xfs
      • log-ignorelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
      • sha1: e52255c96f7a81459ca99de1dff04c6fbfe24689
    • ceph-deploy:
      • conf:
        • client:
          • log file: /var/log/ceph/ceph-$name.$pid.log
        • mon:
          • osd default pool size: 2
    • install:
      • ceph:
        • flavor: default
        • sha1: e52255c96f7a81459ca99de1dff04c6fbfe24689
    • selinux:
      • whitelist:
        • scontext=system_u:system_r:logrotate_t:s0
    • thrashosds:
      • bdev_inject_crash: 2
      • bdev_inject_crash_probability: 0.5
    • workunit:
      • branch: wip-yuri6-testing-2023-01-26-0941
      • sha1: e52255c96f7a81459ca99de1dff04c6fbfe24689
  • owner: scheduled_yuriw@teuthology
  • pid:
  • roles:
    • ['mgr.x', 'mon.a', 'mon.c', 'mds.a', 'mds.c', 'osd.0', 'client.0']
    • ['mgr.y', 'mgr.z', 'mon.b', 'mds.b', 'osd.1', 'osd.2', 'osd.3', 'client.1']
  • sentry_event:
  • status: fail
  • success: False
  • branch: wip-yuri6-testing-2023-01-26-0941
  • seed:
  • sha1: e52255c96f7a81459ca99de1dff04c6fbfe24689
  • subset:
  • suite:
  • suite_branch: wip-yuri6-testing-2023-01-26-0941
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: e52255c96f7a81459ca99de1dff04c6fbfe24689
  • targets:
    • smithi188.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDXaXbmqo9Bot3VXdMgg1+ZO+8qXwrNddToRHe2eEOlV3R4OhiOb7d5AOG+Nxq8lsjrGp7cJ3mWmez2bNIh5H3ai5Jyjgdzz7b+oeDuVzQPV6k5hNhZkcgfeBqYzbsK751pgTszUPimKGH/Xtv4rrAwfc0mBFvYzMcjP7LOmiEM1DlhUOcqjj9MkQ4NfNdmlzOTi4Bop2mRJENou9Ev1uyqx0rBqzw2212XOhEL4/yIvCnb+D26B9Kdd51hNR7W1KFGNCvMeUtHBlU5JUtXQ876fuhqCCH3BAUKDtEtwx0fCJYD8h+U/DOqChYgzG0m3dfSO4KxPOu6V577UbH3dFwTEytdLfYJ6uu8245ExXEb/kUF65vbmchRdGW6Y77SOlmbvQvxsf+UwCnd6/gET3EbUsLdP8vObGbOs3AphhunPWW5e8TxqicDrygRt/PRM1L3IbNRxQJu/rr4tx9PenZDyluK2djtffjxNHpsLd4hjr/DoEo7cE9A7a5JVLbMpI0=
    • smithi195.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDfm037sBJkh0Sx6jnaYW2/EOq6wUA8o3E4wQbzhk2sH379/FnkTo2nafmqHHKys6zv2Q11Bww9oiYZExKKWro/LLy1lcIszmqwycWZjjfwmJkRT+IpK+v/BXlgYCnzGjA3iJK6mYBAo5oBugIxulDIG/iq8F5O3C/ZHnsS0euvUU4HfjV7V3u4gEABruWKWSVpVcVkdIpDX7Q8NMi8qWZoG6BfgM8JYKcrdjiE3sBxOw4acuCb/hmjRZHuoawVi8foeP2MSpv0cruGa7fvfgOAlF+wO9TgebwyZImxCIBE9eJ7OgtJGPStnl6JIpIs94FRFTfaXYMzrybrHtsqFX7Q+BxodB6Uw8PF/qQf5HyLjXwucZ2ROhA456uzaHhxbrnxMEK9oW17DDVVHxxrLB90DDHhzONHc6NSfFuNwlwcsMkjHuCpY/N1GRUaSKiKBirtwex4TV72JuE8CG6769eug/kIxRxGPyyACSy+hJ6seot3MFYC2e1uMqVpsG7zLzE=
  • tasks:
    • internal.check_packages:
    • internal.buildpackages_prep:
    • 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:
      • kdb: True
      • sha1: distro
    • internal.base:
    • internal.archive_upload:
    • internal.archive:
    • internal.coredump:
    • internal.sudo:
    • internal.syslog:
    • internal.timer:
    • pcp:
    • selinux:
    • ansible.cephlab:
    • clock:
    • install:
    • ceph:
      • log-ignorelist:
        • overall HEALTH_
        • \(MGR_DOWN\)
        • \(PG_
        • replacing it with standby
        • No standby daemons available
        • Reduced data availability
        • Degraded data redundancy
        • objects misplaced
        • Synthetic exception in serve
        • influxdb python module not found
        • \(MGR_ZABBIX_
        • foo bar
        • Failed to open Telegraf
        • evicting unresponsive client
        • 1 mgr modules have recently crashed \(RECENT_MGR_MODULE_CRASH\)
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
      • wait-for-scrub: False
      • conf:
        • client:
          • debug client: 20
          • debug mgrc: 20
          • debug ms: 1
        • global:
          • mon election default strategy: 3
        • mds:
          • debug mgrc: 20
        • mgr:
          • debug client: 20
          • debug mgr: 20
          • debug ms: 1
          • mgr ttl cache expire seconds: 5
        • mon:
          • debug mon: 20
          • debug ms: 1
          • debug paxos: 20
        • osd:
          • bluestore block size: 96636764160
          • bluestore compression algorithm: zstd
          • bluestore compression mode: aggressive
          • bluestore fsck on mount: True
          • debug bluefs: 20
          • debug bluestore: 20
          • debug mgrc: 20
          • debug ms: 1
          • debug osd: 20
          • debug rocksdb: 10
          • mon osd backfillfull_ratio: 0.85
          • mon osd full ratio: 0.9
          • mon osd nearfull ratio: 0.8
          • osd failsafe full ratio: 0.95
          • osd objectstore: bluestore
      • flavor: default
      • fs: xfs
      • sha1: e52255c96f7a81459ca99de1dff04c6fbfe24689
      • cluster: ceph
    • cephfs_test_runner:
      • fail_on_skip: False
      • modules:
        • tasks.mgr.test_module_selftest
  • teuthology_branch: main
  • verbose: True
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2023-01-27 01:20:00
  • started: 2023-01-28 02:50:28
  • updated: 2023-01-28 03:32:04
  • status_class: danger
  • runtime: 0:41:36
  • wait_time: 0:09:56