IGT-Version: 1.20-g7440741 (x86_64) (Linux: 4.15.0-rc3-drm-tip-ww50-commit-62d9383+ x86_64)
(gem_exec_schedule:1865) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(gem_exec_schedule:1865) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1865) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
Using Execlists submission
Has kernel scheduler
 - With priority sorting
 - With preemption enabled
(gem_exec_schedule:1865) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) && has_known_intel_chipset(fd)
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: err == 0
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_mmap__has_wc(fd)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1865) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1865) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1865) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1865) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1865) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1865) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1865) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1865) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_has_execlists(fd)
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1865) igt-core-DEBUG: Starting subtest: pi-ringfull-blt
(gem_exec_schedule:1865) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1865) DEBUG: Filled low-priority ring with 199 batches
(gem_exec_schedule:1865) DEBUG: LP parent executing
(gem_exec_schedule:1865) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1865) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1865) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1865) CRITICAL: High priority child unable to submit within 10ms
Subtest pi-ringfull-blt failed.
**** DEBUG ****
(gem_exec_schedule:1865) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1865) DEBUG: Filled low-priority ring with 199 batches
(gem_exec_schedule:1865) DEBUG: LP parent executing
(gem_exec_schedule:1865) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1865) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1865) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1865) CRITICAL: High priority child unable to submit within 10ms
(gem_exec_schedule:1865) igt-core-INFO: Stack trace:
(gem_exec_schedule:1865) igt-core-INFO:   #0 [__igt_fail_assert+0x101]
(gem_exec_schedule:1865) igt-core-INFO:   #1 [__real_main993+0x235d]
(gem_exec_schedule:1865) igt-core-INFO:   #2 [main+0x23]
(gem_exec_schedule:1865) igt-core-INFO:   #3 [__libc_start_main+0xf1]
(gem_exec_schedule:1865) igt-core-INFO:   #4 [_start+0x29]
(gem_exec_schedule:1865) igt-core-INFO:   #5 [<unknown>+0x29]
****  END  ****
Stack trace:
  #0 [__igt_fail_assert+0x101]
  #1 [__real_main993+0x235d]
  #2 [main+0x23]
  #3 [__libc_start_main+0xf1]
  #4 [_start+0x29]
  #5 [<unknown>+0x29]
Subtest pi-ringfull-blt: FAIL (0.059s)
(gem_exec_schedule:1874) DEBUG: Creating HP context
(gem_exec_schedule:1874) DEBUG: HP child executing
(gem_exec_schedule:1865) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1865) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1865) igt-core-DEBUG: Exiting with status code 99
(gem_exec_schedule:1865) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
IGT-Version: 1.20-g7440741 (x86_64) (Linux: 4.15.0-rc3-drm-tip-ww50-commit-62d9383+ x86_64)
(gem_exec_schedule:1877) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(gem_exec_schedule:1877) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1877) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
Using Execlists submission
Has kernel scheduler
 - With priority sorting
 - With preemption enabled
(gem_exec_schedule:1877) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) && has_known_intel_chipset(fd)
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: err == 0
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_mmap__has_wc(fd)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1877) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1877) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1877) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1877) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1877) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1877) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1877) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1877) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_has_execlists(fd)
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1877) igt-core-DEBUG: Starting subtest: pi-ringfull-bsd
(gem_exec_schedule:1877) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1877) DEBUG: Filled low-priority ring with 199 batches
(gem_exec_schedule:1877) DEBUG: LP parent executing
(gem_exec_schedule:1877) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1877) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1877) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1877) CRITICAL: High priority child unable to submit within 10ms
Subtest pi-ringfull-bsd failed.
**** DEBUG ****
(gem_exec_schedule:1877) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1877) DEBUG: Filled low-priority ring with 199 batches
(gem_exec_schedule:1877) DEBUG: LP parent executing
(gem_exec_schedule:1877) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1877) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1877) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1877) CRITICAL: High priority child unable to submit within 10ms
(gem_exec_schedule:1877) igt-core-INFO: Stack trace:
(gem_exec_schedule:1877) igt-core-INFO:   #0 [__igt_fail_assert+0x101]
(gem_exec_schedule:1877) igt-core-INFO:   #1 [__real_main993+0x235d]
(gem_exec_schedule:1877) igt-core-INFO:   #2 [main+0x23]
(gem_exec_schedule:1877) igt-core-INFO:   #3 [__libc_start_main+0xf1]
(gem_exec_schedule:1877) igt-core-INFO:   #4 [_start+0x29]
(gem_exec_schedule:1877) igt-core-INFO:   #5 [<unknown>+0x29]
****  END  ****
Stack trace:
  #0 [__igt_fail_assert+0x101]
  #1 [__real_main993+0x235d]
  #2 [main+0x23]
  #3 [__libc_start_main+0xf1]
  #4 [_start+0x29]
  #5 [<unknown>+0x29]
Subtest pi-ringfull-bsd: FAIL (0.054s)
(gem_exec_schedule:1883) DEBUG: Creating HP context
(gem_exec_schedule:1883) DEBUG: HP child executing
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1877) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1877) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1877) igt-core-DEBUG: Exiting with status code 99
(gem_exec_schedule:1877) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
IGT-Version: 1.20-g7440741 (x86_64) (Linux: 4.15.0-rc3-drm-tip-ww50-commit-62d9383+ x86_64)
(gem_exec_schedule:1885) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(gem_exec_schedule:1885) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1885) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
Using Execlists submission
Has kernel scheduler
 - With priority sorting
 - With preemption enabled
(gem_exec_schedule:1885) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) && has_known_intel_chipset(fd)
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: err == 0
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_mmap__has_wc(fd)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1885) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1885) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1885) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1885) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1885) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1885) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1885) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1885) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_has_execlists(fd)
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1885) igt-core-DEBUG: Starting subtest: pi-ringfull-default
(gem_exec_schedule:1885) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1885) DEBUG: Filled low-priority ring with 153 batches
(gem_exec_schedule:1885) DEBUG: LP parent executing
(gem_exec_schedule:1885) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1885) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1885) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1885) CRITICAL: High priority child unable to submit within 10ms
Subtest pi-ringfull-default failed.
**** DEBUG ****
(gem_exec_schedule:1885) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1885) DEBUG: Filled low-priority ring with 153 batches
(gem_exec_schedule:1885) DEBUG: LP parent executing
(gem_exec_schedule:1885) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1885) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1885) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1885) CRITICAL: High priority child unable to submit within 10ms
(gem_exec_schedule:1885) igt-core-INFO: Stack trace:
(gem_exec_schedule:1885) igt-core-INFO:   #0 [__igt_fail_assert+0x101]
(gem_exec_schedule:1885) igt-core-INFO:   #1 [__real_main993+0x235d]
(gem_exec_schedule:1885) igt-core-INFO:   #2 [main+0x23]
(gem_exec_schedule:1885) igt-core-INFO:   #3 [__libc_start_main+0xf1]
(gem_exec_schedule:1885) igt-core-INFO:   #4 [_start+0x29]
(gem_exec_schedule:1885) igt-core-INFO:   #5 [<unknown>+0x29]
****  END  ****
Stack trace:
  #0 [__igt_fail_assert+0x101]
  #1 [__real_main993+0x235d]
  #2 [main+0x23]
  #3 [__libc_start_main+0xf1]
  #4 [_start+0x29]
  #5 [<unknown>+0x29]
Subtest pi-ringfull-default: FAIL (0.054s)
(gem_exec_schedule:1891) DEBUG: Creating HP context
(gem_exec_schedule:1891) DEBUG: HP child executing
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1885) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1885) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1885) igt-core-DEBUG: Exiting with status code 99
(gem_exec_schedule:1885) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
IGT-Version: 1.20-g7440741 (x86_64) (Linux: 4.15.0-rc3-drm-tip-ww50-commit-62d9383+ x86_64)
(gem_exec_schedule:1894) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(gem_exec_schedule:1894) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1894) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
Using Execlists submission
Has kernel scheduler
 - With priority sorting
 - With preemption enabled
(gem_exec_schedule:1894) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) && has_known_intel_chipset(fd)
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: err == 0
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_mmap__has_wc(fd)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1894) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1894) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1894) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1894) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1894) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1894) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1894) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1894) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_has_execlists(fd)
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1894) igt-core-DEBUG: Starting subtest: pi-ringfull-render
(gem_exec_schedule:1894) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1894) DEBUG: Filled low-priority ring with 153 batches
(gem_exec_schedule:1894) DEBUG: LP parent executing
(gem_exec_schedule:1894) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1894) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1894) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1894) CRITICAL: High priority child unable to submit within 10ms
Subtest pi-ringfull-render failed.
**** DEBUG ****
(gem_exec_schedule:1894) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1894) DEBUG: Filled low-priority ring with 153 batches
(gem_exec_schedule:1894) DEBUG: LP parent executing
(gem_exec_schedule:1894) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1894) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1894) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1894) CRITICAL: High priority child unable to submit within 10ms
(gem_exec_schedule:1894) igt-core-INFO: Stack trace:
(gem_exec_schedule:1894) igt-core-INFO:   #0 [__igt_fail_assert+0x101]
(gem_exec_schedule:1894) igt-core-INFO:   #1 [__real_main993+0x235d]
(gem_exec_schedule:1894) igt-core-INFO:   #2 [main+0x23]
(gem_exec_schedule:1894) igt-core-INFO:   #3 [__libc_start_main+0xf1]
(gem_exec_schedule:1894) igt-core-INFO:   #4 [_start+0x29]
(gem_exec_schedule:1894) igt-core-INFO:   #5 [<unknown>+0x29]
****  END  ****
Stack trace:
  #0 [__igt_fail_assert+0x101]
  #1 [__real_main993+0x235d]
  #2 [main+0x23]
  #3 [__libc_start_main+0xf1]
  #4 [_start+0x29]
  #5 [<unknown>+0x29]
Subtest pi-ringfull-render: FAIL (0.054s)
(gem_exec_schedule:1900) DEBUG: Creating HP context
(gem_exec_schedule:1900) DEBUG: HP child executing
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1894) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1894) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1894) igt-core-DEBUG: Exiting with status code 99
(gem_exec_schedule:1894) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
IGT-Version: 1.20-g7440741 (x86_64) (Linux: 4.15.0-rc3-drm-tip-ww50-commit-62d9383+ x86_64)
(gem_exec_schedule:1902) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(gem_exec_schedule:1902) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1902) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
Using Execlists submission
Has kernel scheduler
 - With priority sorting
 - With preemption enabled
(gem_exec_schedule:1902) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) && has_known_intel_chipset(fd)
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: err == 0
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_mmap__has_wc(fd)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1902) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1902) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1902) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1902) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Last errno: 9, Bad file descriptor
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1902) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1902) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_can_store_dword(fd, e->exec_id) | e->flags
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1902) i915/gem-context-DEBUG: Test requirement passed: has_ban_period || has_bannable
(gem_exec_schedule:1902) igt-gt-DEBUG: Test requirement passed: has_gpu_reset(fd)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_enabled(fd)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_ctx_priority(fd)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_has_execlists(fd)
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
Test requirement not met in function gem_require_ring, file ioctl_wrappers.c:1460:
Test requirement: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1902) ioctl-wrappers-DEBUG: Test requirement passed: gem_has_ring(fd, ring)
(gem_exec_schedule:1902) DEBUG: Test requirement passed: gem_scheduler_has_preemption(fd)
(gem_exec_schedule:1902) igt-core-DEBUG: Starting subtest: pi-ringfull-vebox
(gem_exec_schedule:1902) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1902) DEBUG: Filled low-priority ring with 199 batches
(gem_exec_schedule:1902) DEBUG: LP parent executing
(gem_exec_schedule:1902) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1902) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1902) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1902) CRITICAL: High priority child unable to submit within 10ms
Subtest pi-ringfull-vebox failed.
**** DEBUG ****
(gem_exec_schedule:1902) drmtest-DEBUG: Test requirement passed: !(fd<0)
(gem_exec_schedule:1902) DEBUG: Filled low-priority ring with 199 batches
(gem_exec_schedule:1902) DEBUG: LP parent executing
(gem_exec_schedule:1902) CRITICAL: Test assertion failure function test_pi_ringfull, file gem_exec_schedule.c:982:
(gem_exec_schedule:1902) CRITICAL: Failed assertion: result[2]
(gem_exec_schedule:1902) CRITICAL: Last errno: 4, Interrupted system call
(gem_exec_schedule:1902) CRITICAL: High priority child unable to submit within 10ms
(gem_exec_schedule:1902) igt-core-INFO: Stack trace:
(gem_exec_schedule:1902) igt-core-INFO:   #0 [__igt_fail_assert+0x101]
(gem_exec_schedule:1902) igt-core-INFO:   #1 [__real_main993+0x235d]
(gem_exec_schedule:1902) igt-core-INFO:   #2 [main+0x23]
(gem_exec_schedule:1902) igt-core-INFO:   #3 [__libc_start_main+0xf1]
(gem_exec_schedule:1902) igt-core-INFO:   #4 [_start+0x29]
(gem_exec_schedule:1902) igt-core-INFO:   #5 [<unknown>+0x29]
****  END  ****
Stack trace:
  #0 [__igt_fail_assert+0x101]
  #1 [__real_main993+0x235d]
  #2 [main+0x23]
  #3 [__libc_start_main+0xf1]
  #4 [_start+0x29]
  #5 [<unknown>+0x29]
Subtest pi-ringfull-vebox: FAIL (0.054s)
(gem_exec_schedule:1908) DEBUG: Creating HP context
(gem_exec_schedule:1908) DEBUG: HP child executing
(gem_exec_schedule:1902) igt-core-DEBUG: Exiting with status code 99
(gem_exec_schedule:1902) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'